[INFO] cloning repository https://github.com/SirJonasM/fpga-router
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/SirJonasM/fpga-router" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FSirJonasM%2Ffpga-router", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FSirJonasM%2Ffpga-router'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 0ae329472187a6f6e40674951a89ea026f5ceaf0
[INFO] testing SirJonasM/fpga-router against master#1f7f8ea0721a3b1eb73e6c6d25cccb371434b320 for pr-154065
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FSirJonasM%2Ffpga-router" "/workspace/builds/worker-3-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/SirJonasM/fpga-router
[INFO] finished tweaking git repo https://github.com/SirJonasM/fpga-router
[INFO] tweaked toml for git repo https://github.com/SirJonasM/fpga-router written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/SirJonasM/fpga-router on toolchain 1f7f8ea0721a3b1eb73e6c6d25cccb371434b320
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/SirJonasM/fpga-router already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded which v8.0.2
[INFO] [stderr]   Downloaded clearscreen v4.0.6
[INFO] [stderr]   Downloaded nix v0.31.2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] f730e3e480f9dadf740a45c1904452e687d9e231a414e967e45d31376bc0f62e
[INFO] running `Command { std: "docker" "start" "-a" "f730e3e480f9dadf740a45c1904452e687d9e231a414e967e45d31376bc0f62e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f730e3e480f9dadf740a45c1904452e687d9e231a414e967e45d31376bc0f62e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f730e3e480f9dadf740a45c1904452e687d9e231a414e967e45d31376bc0f62e", kill_on_drop: false }`
[INFO] [stdout] f730e3e480f9dadf740a45c1904452e687d9e231a414e967e45d31376bc0f62e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 59217efd8a9dd5580f7832e234e4027819290bfa33680df981d5794a8229e7da
[INFO] running `Command { std: "docker" "start" "-a" "59217efd8a9dd5580f7832e234e4027819290bfa33680df981d5794a8229e7da", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.183
[INFO] [stderr]    Compiling siphasher v1.0.2
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling nix v0.31.2
[INFO] [stderr]    Compiling minimal-lexical v0.2.1
[INFO] [stderr]    Compiling crypto-common v0.1.7
[INFO] [stderr]    Compiling clap_builder v4.5.54
[INFO] [stderr]    Compiling csv-core v0.1.13
[INFO] [stderr]    Compiling anyhow v1.0.102
[INFO] [stderr]    Compiling testing_utils v0.1.0 (/opt/rustwide/workdir/testing_utils)
[INFO] [stderr]    Compiling rayon v1.11.0
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling phf_shared v0.11.3
[INFO] [stderr]    Compiling phf v0.11.3
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling phf_generator v0.11.3
[INFO] [stderr]    Compiling phf_codegen v0.11.3
[INFO] [stderr]    Compiling terminfo v0.9.0
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling which v8.0.2
[INFO] [stderr]    Compiling rand_core v0.9.3
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling csv v1.4.0
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling clap_derive v4.5.49
[INFO] [stderr]    Compiling clap v4.5.54
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling clearscreen v4.0.6
[INFO] [stderr]    Compiling router v0.1.0 (/opt/rustwide/workdir/engine)
[INFO] [stderr]    Compiling router-cli v0.1.0 (/opt/rustwide/workdir/cli)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 23.66s
[INFO] running `Command { std: "docker" "inspect" "59217efd8a9dd5580f7832e234e4027819290bfa33680df981d5794a8229e7da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "59217efd8a9dd5580f7832e234e4027819290bfa33680df981d5794a8229e7da", kill_on_drop: false }`
[INFO] [stdout] 59217efd8a9dd5580f7832e234e4027819290bfa33680df981d5794a8229e7da
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2586de7ba1966d63da6057cab0f9aab076923e7959a84adda887381bea76c05a
[INFO] running `Command { std: "docker" "start" "-a" "2586de7ba1966d63da6057cab0f9aab076923e7959a84adda887381bea76c05a", kill_on_drop: false }`
[INFO] [stderr]    Compiling testing_utils v0.1.0 (/opt/rustwide/workdir/testing_utils)
[INFO] [stderr]    Compiling router v0.1.0 (/opt/rustwide/workdir/engine)
[INFO] [stderr]    Compiling router-cli v0.1.0 (/opt/rustwide/workdir/cli)
[INFO] [stdout] warning: unused variable: `result`
[INFO] [stdout]    --> engine/tests/routing_tests.rs:111:9
[INFO] [stdout]     |
[INFO] [stdout] 111 |     let result = create_fasm(&net_list).unwrap();
[INFO] [stdout]     |         ^^^^^^ help: if this is intentional, prefix it with an underscore: `_result`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.81s
[INFO] running `Command { std: "docker" "inspect" "2586de7ba1966d63da6057cab0f9aab076923e7959a84adda887381bea76c05a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2586de7ba1966d63da6057cab0f9aab076923e7959a84adda887381bea76c05a", kill_on_drop: false }`
[INFO] [stdout] 2586de7ba1966d63da6057cab0f9aab076923e7959a84adda887381bea76c05a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 10240a96c3ba1663dcda2f393874257c01cfbb7e8b4e2f35430be1a64e3d9117
[INFO] running `Command { std: "docker" "start" "-a" "10240a96c3ba1663dcda2f393874257c01cfbb7e8b4e2f35430be1a64e3d9117", kill_on_drop: false }`
[INFO] [stderr] warning: unused variable: `result`
[INFO] [stderr]    --> engine/tests/routing_tests.rs:111:9
[INFO] [stderr]     |
[INFO] [stderr] 111 |     let result = create_fasm(&net_list).unwrap();
[INFO] [stderr]     |         ^^^^^^ help: if this is intentional, prefix it with an underscore: `_result`
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `router` (test "routing_tests") generated 1 warning (run `cargo fix --test "routing_tests" -p router` to apply 1 suggestion)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/router-792e0a6d9245670c)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test graph::fabric_graph::test::test_parse_pips_file_error_accessing_file ... ok
[INFO] [stdout] test graph::node::test::test_from_str_coords_fail_y ... ok
[INFO] [stdout] test graph::node::test::test_update_costs_congested ... ok
[INFO] [stdout] test graph::node::test::test_update_costs_uncongested ... ok
[INFO] [stdout] test graph::parser::test::test_parse_from_pips_line_failure_line_format ... ok
[INFO] [stdout] test graph::node::test::test_parse_node ... ok
[INFO] [stdout] test graph::parser::test::test_parse_from_pips_line_failure_start_node ... ok
[INFO] [stdout] test graph::parser::test::test_parse_from_pips_line_success ... ok
[INFO] [stdout] test graph::parser::test::test_parse_from_pips_line_failure_end_node ... ok
[INFO] [stdout] test graph::node::test::test_from_str_coords_fail_x ... ok
[INFO] [stdout] test graph::node::test::test_calculate_costs ... ok
[INFO] [stdout] test graph::fabric_graph::test::test_parse_pips_file ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.83s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/routing_tests.rs (/opt/rustwide/target/debug/deps/routing_tests-42cebb68c5e36cc2)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test test_create_test_bad_destinations ... ok
[INFO] [stdout] test test_create_test ... ok
[INFO] [stdout] test test_create_test_bad_percentage ... ok
[INFO] [stdout] test test_routing_simple ... ok
[INFO] [stdout] test test_routing_simple_logging ... ok
[INFO] [stdout] test test_create_fasm ... ok
[INFO] [stdout] test test_routing_steiner ... ok
[INFO] [stderr] error: test failed, to rerun pass `-p router --test routing_tests`
[INFO] [stdout] test test_routing_simple_steiner ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test_routing_simple_steiner stdout ----
[INFO] [stdout] RouterIteration(IterationResult { iteration: 0, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 24, longest_path: ("X2Y1.LB_O", "X1Y4.LC_I3"), longest_path_cost: 25.0, average_path_cost: 13.701755, total_wire_use: 634, wire_reuse: 1.1188768, duration: 260.726788ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 1, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 22, longest_path: ("X2Y1.LB_O", "X1Y4.LC_I3"), longest_path_cost: 25.0, average_path_cost: 13.701755, total_wire_use: 626, wire_reuse: 1.1392914, duration: 214.965599ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 2, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 16, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.877193, total_wire_use: 622, wire_reuse: 1.1544042, duration: 211.320559ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 3, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 14, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.912281, total_wire_use: 632, wire_reuse: 1.1451735, duration: 221.560818ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 4, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 14, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.912281, total_wire_use: 638, wire_reuse: 1.1264791, duration: 218.405169ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 5, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 10, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.947369, total_wire_use: 622, wire_reuse: 1.1605961, duration: 211.030849ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 6, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 207.383779ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 7, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 12, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 638, wire_reuse: 1.1422433, duration: 206.390628ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 8, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 8, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.947369, total_wire_use: 630, wire_reuse: 1.141587, duration: 199.185548ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 9, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 8, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.947369, total_wire_use: 630, wire_reuse: 1.141587, duration: 202.834958ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 10, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 210.009409ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 11, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 209.741659ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 12, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 220.188229ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 13, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 212.345938ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 14, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 202.729639ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 15, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1514838, duration: 213.621438ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 16, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 620, wire_reuse: 1.1670783, duration: 217.398939ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 17, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 620, wire_reuse: 1.1670783, duration: 225.499799ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 18, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 620, wire_reuse: 1.1670783, duration: 210.485738ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 19, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 620, wire_reuse: 1.1670783, duration: 211.084648ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 20, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 204.508269ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 21, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1514838, duration: 210.993439ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 22, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1514838, duration: 205.803559ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 23, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 620, wire_reuse: 1.1670783, duration: 190.403229ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 24, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1514838, duration: 187.770439ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 25, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1514838, duration: 185.558329ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 26, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1414331, duration: 180.795439ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 27, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1514838, duration: 182.835989ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 28, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1414331, duration: 186.166119ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 29, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1514838, duration: 194.172469ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 30, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1514838, duration: 215.048688ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 31, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1514838, duration: 216.409179ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 32, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1514838, duration: 202.499469ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 33, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 186.603649ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 34, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 190.073229ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 35, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1414331, duration: 200.878479ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 36, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1414331, duration: 200.325649ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 37, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1414331, duration: 199.965539ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 38, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 632, wire_reuse: 1.1414331, duration: 199.656698ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 39, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 620, wire_reuse: 1.1670783, duration: 194.869988ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 40, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 620, wire_reuse: 1.1670783, duration: 200.326599ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 41, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 195.055539ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 42, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 193.262409ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 43, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 188.693859ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 44, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 197.008329ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 45, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 6, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 13.982456, total_wire_use: 644, wire_reuse: 1.1258385, duration: 213.245589ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 46, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 206.806458ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 47, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 196.87977ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 48, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 197.99607ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 49, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 201.085208ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 50, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 202.300389ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 51, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 192.419429ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 52, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 197.105529ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 53, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 193.347529ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 54, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 195.424239ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 55, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 207.811229ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 56, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 208.066969ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 57, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 211.703209ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 58, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 200.600009ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 59, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 198.994119ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 60, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 194.729819ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 61, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 197.831999ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 62, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 197.682429ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 63, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 197.471929ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 64, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 191.729789ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 65, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 198.996799ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 66, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 194.646979ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 67, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 196.902069ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 68, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 195.276469ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 69, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 197.399809ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 70, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 210.892339ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 71, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 194.390269ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 72, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 195.718319ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 73, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 188.732689ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 74, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 188.983159ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 75, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 188.432959ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 76, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 189.541279ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 77, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 208.029218ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 78, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 199.479819ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 79, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 188.282729ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 80, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 188.565169ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 81, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 185.035889ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 82, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 188.051469ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 83, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 186.883979ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 84, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 223.058739ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 85, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 225.365018ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 86, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 219.997529ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 87, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 217.427499ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 88, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 219.699429ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 89, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 213.497488ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 90, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 221.217418ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 91, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 215.076918ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 92, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 216.624169ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 93, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 216.215059ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 94, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 217.933008ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 95, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 213.070539ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 96, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 209.730799ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 97, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 205.625159ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 98, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 211.949819ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 99, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 212.046098ms })
[INFO] [stdout] RouterIteration(IterationResult { iteration: 100, test_case: Config { id: 1, hist_factor: 0.1, max_iterations: 100 }, conflicts: 4, longest_path: ("X3Y1.LA_O", "X2Y4.LC_I1"), longest_path_cost: 29.0, average_path_cost: 14.157895, total_wire_use: 640, wire_reuse: 1.1405977, duration: 211.852928ms })
[INFO] [stdout] 
[INFO] [stdout] thread 'test_routing_simple_steiner' (36) panicked at engine/tests/routing_tests.rs:64:5:
[INFO] [stdout] assertion failed: result.is_ok()
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x609f53aac42a - std[f92b4c606f291077]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x609f53aac42a - std[f92b4c606f291077]::backtrace_rs::backtrace::trace_unsynchronized::<std[f92b4c606f291077]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x609f53aac42a - std[f92b4c606f291077]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x609f53aac42a - <<std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[786f478f706679df]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x609f53ac189a - <core[786f478f706679df]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x609f53ac189a - core[786f478f706679df]::fmt::write
[INFO] [stdout]    6:     0x609f53ab0d02 - std[f92b4c606f291077]::io::default_write_fmt::<alloc[64763625b5a07cdb]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x609f53ab0d02 - <alloc[64763625b5a07cdb]::vec::Vec<u8> as std[f92b4c606f291077]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x609f53a8b1cf - <std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x609f53a8b1cf - std[f92b4c606f291077]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x609f53aa4919 - std[f92b4c606f291077]::panicking::default_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x609f5393821c - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x609f5393821c - test[20e1f0ae6cad7a17]::test_main_with_exit_callback::<test[20e1f0ae6cad7a17]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x609f53aa4b92 - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x609f53aa4b92 - std[f92b4c606f291077]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x609f53a8b2ba - std[f92b4c606f291077]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x609f53a82c29 - std[f92b4c606f291077]::sys::backtrace::__rust_end_short_backtrace::<std[f92b4c606f291077]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x609f53a8bf9d - __rustc[8241495c18a89d70]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x609f53ac202c - core[786f478f706679df]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x609f53ac1ff2 - core[786f478f706679df]::panicking::panic
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:150:5
[INFO] [stdout]   20:     0x609f53924bc7 - routing_tests[c2049ea61b86f050]::test_routing_simple_steiner
[INFO] [stdout]                                at /opt/rustwide/workdir/engine/tests/routing_tests.rs:64:5
[INFO] [stdout]   21:     0x609f53922617 - routing_tests[c2049ea61b86f050]::test_routing_simple_steiner::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/engine/tests/routing_tests.rs:54:33
[INFO] [stdout]   22:     0x609f5392c1f6 - <routing_tests[c2049ea61b86f050]::test_routing_simple_steiner::{closure#0} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x609f5392c2fb - <fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x609f5392c2fb - test[20e1f0ae6cad7a17]::__rust_begin_short_backtrace::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:663:18
[INFO] [stdout]   25:     0x609f53938ceb - test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:74
[INFO] [stdout]   26:     0x609f53938ceb - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   27:     0x609f53938ceb - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   28:     0x609f53938ceb - std[f92b4c606f291077]::panicking::catch_unwind::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   29:     0x609f53938ceb - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   30:     0x609f53938ceb - test[20e1f0ae6cad7a17]::run_test_in_process
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:27
[INFO] [stdout]   31:     0x609f53938ceb - test[20e1f0ae6cad7a17]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:607:43
[INFO] [stdout]   32:     0x609f53934404 - test[20e1f0ae6cad7a17]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:637:41
[INFO] [stdout]   33:     0x609f53934404 - std[f92b4c606f291077]::sys::backtrace::__rust_begin_short_backtrace::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   34:     0x609f5393b8f2 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   35:     0x609f5393b8f2 - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   36:     0x609f5393b8f2 - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   37:     0x609f5393b8f2 - std[f92b4c606f291077]::panicking::catch_unwind::<(), core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   38:     0x609f5393b8f2 - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   39:     0x609f5393b8f2 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   40:     0x609f5393b8f2 - <std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x609f53aabd2f - <alloc[64763625b5a07cdb]::boxed::Box<dyn core[786f478f706679df]::ops::function::FnOnce<(), Output = ()> + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   42:     0x609f53aabd2f - <std[f92b4c606f291077]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   43:     0x7fd71a877aa4 - <unknown>
[INFO] [stdout]   44:     0x7fd71a904a64 - clone
[INFO] [stdout]   45:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test_routing_simple_steiner
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 7 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 22.18s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "10240a96c3ba1663dcda2f393874257c01cfbb7e8b4e2f35430be1a64e3d9117", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "10240a96c3ba1663dcda2f393874257c01cfbb7e8b4e2f35430be1a64e3d9117", kill_on_drop: false }`
[INFO] [stdout] 10240a96c3ba1663dcda2f393874257c01cfbb7e8b4e2f35430be1a64e3d9117
